← Index
NYTProf Performance Profile   
For starman worker -M FindBin --max-requests 50 --workers 2 --user=kohadev-koha --group kohadev-koha --pid /var/run/koha/kohadev/plack.pid --daemonize --access-log /var/log/koha/kohadev/plack.log --error-log /var/log/koha/kohadev/plack-error.log -E deployment --socket /var/run/koha/kohadev/plack.sock /etc/koha/sites/kohadev/plack.psgi
  Run on Fri Jan 8 14:16:49 2016
Reported on Fri Jan 8 14:23:09 2016

Filename(eval 1112)[/usr/share/perl5/CGI.pm:932]
StatementsExecuted 4 statements in 11µs
Eval Invoked At/usr/share/perl5/CGI.pm line 932
Sibling evals1, 2, 3, 4
Subroutines
Calls P F Exclusive
Time
Inclusive
Time
Subroutine
242143µs43µsCGI::::CORE:regcompCGI::CORE:regcomp (opcode)
214236µs36µsCGI::::CORE:matchCGI::CORE:match (opcode)
183222µs22µsCGI::::CORE:substCGI::CORE:subst (opcode)
21115µs18µsCGI::::cacheCGI::cache
6119µs9µsCGI::::CORE:substcontCGI::CORE:substcont (opcode)
Call graph for these subroutines as a Graphviz dot language file.
Line State
ments
Time
on line
Calls Time
in subs
Code
1
# spent 18µs (15+2) within CGI::cache which was called 2 times, avg 9µs/call: # 2 times (15µs+2µs) by CGI::header at line 76 of (eval 1110)[CGI.pm:932], avg 9µs/call
package CGI; sub cache {
214µs35µs my($self,$new_value) = self_or_default(@_);
# spent 5µs making 3 calls to CGI::self_or_default, avg 2µs/call
312µs $new_value = '' unless $new_value;
41400ns if ($new_value ne '') {
5 $self->{'cache'} = $new_value;
6 }
715µs return $self->{'cache'};
8}
9
10;
 
# spent 36µs within CGI::CORE:match which was called 21 times, avg 2µs/call: # 12 times (16µs+0s) by CGI::header at line 31 of (eval 1110)[CGI.pm:932], avg 1µs/call # 3 times (17µs+0s) by CGI::header at line 50 of (eval 1110)[CGI.pm:932], avg 6µs/call # 3 times (2µs+0s) by CGI::header at line 54 of (eval 1110)[CGI.pm:932], avg 633ns/call # 3 times (2µs+0s) by CGI::unescapeHTML at line 6 of (eval 1111)[CGI.pm:932], avg 567ns/call
sub CGI::CORE:match; # opcode
# spent 43µs within CGI::CORE:regcomp which was called 24 times, avg 2µs/call: # 12 times (22µs+0s) by CGI::header at line 28 of (eval 1110)[CGI.pm:932], avg 2µs/call # 12 times (22µs+0s) by CGI::header at line 31 of (eval 1110)[CGI.pm:932], avg 2µs/call
sub CGI::CORE:regcomp; # opcode
# spent 22µs within CGI::CORE:subst which was called 18 times, avg 1µs/call: # 12 times (8µs+0s) by CGI::header at line 28 of (eval 1110)[CGI.pm:932], avg 700ns/call # 3 times (10µs+0s) by CGI::header at line 51 of (eval 1110)[CGI.pm:932], avg 3µs/call # 3 times (3µs+0s) by CGI::unescapeHTML at line 9 of (eval 1111)[CGI.pm:932], avg 1µs/call
sub CGI::CORE:subst; # opcode
# spent 9µs within CGI::CORE:substcont which was called 6 times, avg 1µs/call: # 6 times (9µs+0s) by CGI::header at line 51 of (eval 1110)[CGI.pm:932], avg 1µs/call
sub CGI::CORE:substcont; # opcode